**** dT 0.000 * top TEST ../../../../bin/vinyltest/tests/c00057.vtc starting **** top extmacro def pkg_version=trunk **** top extmacro def pkg_branch=trunk **** top extmacro def pwd=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest **** top extmacro def date(...) **** top extmacro def string(...) **** top extmacro def localhost=127.0.0.1 **** top extmacro def bad_backend=127.0.0.1:48564 **** top extmacro def listen_addr=127.0.0.1:0 **** top extmacro def bad_ip=192.0.2.255 **** top extmacro def topbuild=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub **** top extmacro def topsrc=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/../.. **** top macro def testdir=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/../../../../bin/vinyltest/tests **** top macro def tmpdir=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7 **** top macro def vtcid=vtc.405267.76cbfae7 ** top === vtest "test sigsegv handler" * top VTEST test sigsegv handler ** top === feature !asan ** top === server s1 { **** dT 0.001 ** s1 Starting server **** s1 macro def s1_addr=127.0.0.1 **** s1 macro def s1_port=59512 **** s1 macro def s1_sock=127.0.0.1:59512 * s1 Listen on 127.0.0.1:59512 **** dT 0.002 ** top === vinyl v1 \ ** s1 Started on 127.0.0.1:59512 (1 iterations) **** dT 0.017 ** v1 Launch *** v1 CMD: cd ${pwd} && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 61619' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: -p feature=+no_coredump -p vcc_feature=+allow_inline_c -p thread_pool_stack=128k *** v1 CMD: cd /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 61619' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: -p feature=+no_coredump -p vcc_feature=+allow_inline_c -p thread_pool_stack=128k *** v1 PID: 405331 **** v1 macro def v1_pid=405331 **** v1 macro def v1_name=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1 **** dT 0.069 *** v1 debug|Warning: mlock() of VSM failed: Not owner (1 *** v1 debug|) **** dT 0.073 *** v1 debug|Debug: Version: vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v1 debug|Debug: Platform: -jsolaris,-sdefault,-sdefault,-hcritbit *** v1 debug|200 292 *** v1 debug|----------------------------- *** v1 debug|Vinyl Cache CLI 1.0 *** v1 debug|----------------------------- *** v1 debug|-jsolaris,-sdefault,-sdefault,-hcritbit *** v1 debug|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v1 debug| *** v1 debug|Type 'help' for command list. *** v1 debug|Type 'quit' to close CLI session. *** v1 debug|Type 'start' to launch worker process. *** v1 debug| **** dT 0.169 **** v1 CLIPOLL 1 0x1 0x0 0x0 **** dT 0.170 *** v1 CLI connection fd = 6 *** v1 CLI RX 107 **** v1 CLI RX|sluzazbbbwtfqjwzgpmxijvukxfmvqsp **** v1 CLI RX| **** v1 CLI RX|Authentication required. **** v1 CLI TX|auth 6beb37109b45fccd639efa4301ef9b3de46d5ccf9b158352590ffc588208e869 **** dT 0.171 *** v1 CLI RX 200 **** v1 CLI RX|----------------------------- **** v1 CLI RX|Vinyl Cache CLI 1.0 **** v1 CLI RX|----------------------------- **** v1 CLI RX|-jsolaris,-sdefault,-sdefault,-hcritbit **** v1 CLI RX|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 **** v1 CLI RX| **** v1 CLI RX|Type 'help' for command list. **** v1 CLI RX|Type 'quit' to close CLI session. **** v1 CLI RX|Type 'start' to launch worker process. **** dT 0.172 **** v1 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P **** v1 CLI TX|vcl 4.1; **** v1 CLI TX|backend s1 { .host = "127.0.0.1"; .port = "59512"; } **** v1 CLI TX| **** v1 CLI TX| **** v1 CLI TX|\tC{ **** v1 CLI TX|#include **** v1 CLI TX|#include **** v1 CLI TX|#include **** v1 CLI TX| **** v1 CLI TX|static void _accessor(volatile char *p) { **** v1 CLI TX| p[0] = 'V'; p[1] = '\0'; **** v1 CLI TX| fprintf(stderr, "%p %s\n", p, p); **** v1 CLI TX|} **** v1 CLI TX|static void (*accessor)(volatile char *p) = _accessor; **** v1 CLI TX| **** v1 CLI TX|}C **** v1 CLI TX|\tsub vcl_recv { C{ **** v1 CLI TX|\t #define STKKB 128 **** v1 CLI TX|\t int i; **** v1 CLI TX|\t volatile char overflow[STKKB * 1024]; **** v1 CLI TX| **** v1 CLI TX|\t /* for downwards stack, take care to hit a single guard page */ **** v1 CLI TX|\t for (i = (STKKB - 1) * 1024; i >= 0; i -= 1024) **** v1 CLI TX|\t\taccessor(overflow + i); **** v1 CLI TX|\t /* NOTREACHED */ **** v1 CLI TX|\t sleep(2); **** v1 CLI TX|\t}C } **** v1 CLI TX| **** v1 CLI TX|%XJEIFLH|)Xspa8P **** dT 0.272 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.372 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.472 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.572 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.672 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.772 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.872 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.972 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 1.072 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 1.173 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 1.183 *** v1 CLI RX 200 **** v1 CLI RX|Message from VCC-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|Message from C-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|Message from dlopen: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|VCL compiled. **** v1 CLI TX|vcl.use vcl1 *** v1 CLI RX 200 **** v1 CLI RX|VCL 'vcl1' now active ** v1 Start **** v1 CLI TX|start **** dT 1.199 *** v1 debug|Debug: Child (406345) Started *** v1 debug| **** dT 1.232 *** v1 debug|Child launched OK **** dT 1.233 *** v1 CLI RX 200 *** v1 debug|Info: Child (406345) said Child starts *** v1 wait-running **** v1 CLI TX|status *** v1 debug|Info: Child (406345) said Security: proc_setid missing, uid/gid unchanged **** dT 1.234 *** v1 CLI RX 200 **** v1 CLI RX|Child in state running **** v1 CLI TX|debug.listen_address *** v1 CLI RX 200 **** v1 CLI RX|a0 127.0.0.1 38555 **** v1 CLI TX|debug.xid 1000 *** v1 CLI RX 200 **** v1 CLI RX|XID is 1000 chunk 1 **** v1 CLI TX|debug.listen_address *** v1 CLI RX 200 **** v1 CLI RX|a0 127.0.0.1 38555 ** v1 Listen on 127.0.0.1 38555 **** v1 macro def v1_addr=127.0.0.1 **** v1 macro def v1_port=38555 **** v1 macro def v1_sock=127.0.0.1:38555 **** v1 macro def v1_a0_addr=127.0.0.1 **** v1 macro def v1_a0_port=38555 **** v1 macro def v1_a0_sock=127.0.0.1:38555 **** dT 1.273 **** v1 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1773745221.726507/vgc.so 1auto **** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1773745221.726507/vgc.so" as "vcl1" **** v1 vsl| 0 CLI - Rd vcl.use "vcl1" **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd start **** v1 vsl| 0 Debug - sockopt: Setting SO_LINGER for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPIDLE for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPCNT for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPINTVL for a0=127.0.0.1:38555 **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 38555 **** v1 vsl| 0 CLI - Rd debug.xid 1000 **** v1 vsl| 0 CLI - Wr 200 19 XID is 1000 chunk 1 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 38555 **** dT 1.334 ** top === client c1 { ** c1 Starting client ** c1 Waiting for client ** c1 Started on 127.0.0.1:38555 (1 iterations) *** c1 Connect to 127.0.0.1:38555 **** dT 1.335 *** c1 connected fd 16 from 127.0.0.1 59685 to 127.0.0.1:38555 ** c1 === txreq **** c1 txreq|GET / HTTP/1.1\r **** c1 txreq|Host: 127.0.0.1\r **** c1 txreq|User-Agent: c1\r **** c1 txreq|\r ** c1 === expect_close **** c1 Expecting close (fd = 16) **** dT 1.340 **** c1 fd=16 EOF, as expected *** c1 closing fd 16 ** c1 Ending ** top === delay 3 *** top delaying 3 second(s) **** dT 1.373 **** v1 vsl| 1000 Begin c sess 0 HTTP/1 **** v1 vsl| 1000 SessOpen c 127.0.0.1 59685 a0 127.0.0.1 38555 1773745222.889841 16 **** v1 vsl| 1000 Debug c sockopt: Test confirmed SO_KEEPALIVE non heredity for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Link c req 1001 rxreq **** v1 vsl| 1001 Begin c req 1000 rxreq **** v1 vsl| 1001 Timestamp c Start: 1773745222.890167 0.000000 0.000000 **** v1 vsl| 1001 Timestamp c Req: 1773745222.890167 0.000000 0.000000 **** v1 vsl| 1001 VCL_use c vcl1 **** v1 vsl| 1001 ReqStart c 127.0.0.1 59685 a0 **** v1 vsl| 1001 ReqMethod c GET **** v1 vsl| 1001 ReqURL c / **** v1 vsl| 1001 ReqProtocol c HTTP/1.1 **** v1 vsl| 1001 ReqHeader c Host: 127.0.0.1 **** v1 vsl| 1001 ReqHeader c User-Agent: c1 **** v1 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1 **** v1 vsl| 1001 ReqHeader c Via: 1.1 v1 (Vinyl-Cache/trunk) **** v1 vsl| 1001 VCL_call c RECV **** dT 1.440 *** v1 debug|Error: *** v1 debug|Child (406345) died signal=6 **** dT 1.441 *** v1 debug|Error: *** v1 debug| Child (406345) Panic at: Tue, 17 Mar 2026 11:00:22 GMT *** v1 debug|Wrong turn at ../../../../bin/vinyld/cache/cache_main.c:343: *** v1 debug|Signal 11 (Segmentation Fault) received at fe05919c si_code 1 *** v1 debug|THIS PROBABLY IS A STACK OVERFLOW - check thread_pool_stack parameter *** v1 debug|version = vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4, vrt api = 23.0 *** v1 debug|ident = -jsolaris,-sdefault,-sdefault,-hcritbit,ports *** v1 debug|now = 5957299.910516 (mono), 1773745222.890379 (real) *** v1 debug|Backtrace: *** v1 debug| 8149fb3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vbt_execinfo+0x39 [0x8149fb3] *** v1 debug| 814a1c4: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VBT_format+0x2d [0x814a1c4] *** v1 debug| 80aecdd: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_backtrace+0x34 [0x80aecdd] *** v1 debug| 80af020: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_ic+0x27c [0x80af020] *** v1 debug| 81495b9: /tmp/vtest.gcc13_m32 *** v1 debug|_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VAS_Fail+0x3a [0x81495b9] *** v1 debug| 80a8694: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'child_sigmagic+0x0 [0x80a8694] *** v1 debug| fedfad15: /lib/libc.so.1'__sighndlr+0x15 [0xfedfad15] *** v1 debug| fedee8d1: /lib/libc.so.1'call_user_handler+0x1e7 [0xfedee8d1] *** v1 debug| fedeeaf9: /lib/libc.so.1'sigacthandler+0xfd [0xfedeeaf9] *** v1 debug| ffffffff: [0xffffffff] *** v1 debug| 80d6cec: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vcl_call_method+0x422 [0x80d6cec] *** v1 debug| 80d80d3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCL_recv_method+0x121 [0x80d80d3] *** v1 debug| 80b712b: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cnt_recv+0x3c6 [0x80b712b] *** v1 debug| 80b7f12: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'CNT_Request+0x459 [0x80b7f12] *** v1 debug| 80e622e: /tmp/vtest.gcc13_m32_IPv4_uffix/v *** v1 debug|arnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'HTTP1_Session+0x83b [0x80e622e] *** v1 debug| 80e4ea9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'http1_req+0xe9 [0x80e4ea9] *** v1 debug| 80da7cf: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'Pool_Work_Thread+0x589 [0x80da7cf] *** v1 debug| 80d9682: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'WRK_Thread+0x2a2 [0x80d9682] *** v1 debug| 80da910: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pool_thread+0x81 [0x80da910] *** v1 debug| fedfa97f: /lib/libc.so.1'_thrp_setup+0x7f [0xfedfa97f] *** v1 debug|argv = { *** v1 debug| [0] = \"vinyld\", *** v1 debug| [1] = \"-d\", *** v1 debug| [2] = \"-n\", *** v1 debug| [3] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1\", *** v1 debug| [4] = \"-i\", *** v1 debug| [5] = \"v1\", *** v1 debug| [6] = \"-l\", *** v1 debug| [7] = \"2m\", *** v1 debug| [8] = \"-p\", *** v1 debug| [9] = \"auto_restart=off\", *** v1 debug| [10] = \"-p\", *** v1 debug| [11] = \"syslog_cli_traffic=off\", *** v1 debug| [12] = \"-p\", *** v1 debug| [13] = \"thread *** v1 debug|_pool_min=10\", *** v1 debug| [14] = \"-p\", *** v1 debug| [15] = \"debug=+vtc_mode\", *** v1 debug| [16] = \"-p\", *** v1 debug| [17] = \"vsl_mask=+Debug,+H2RxHdr,+H2RxBody\", *** v1 debug| [18] = \"-p\", *** v1 debug| [19] = \"h2_initial_window_size=1m\", *** v1 debug| [20] = \"-p\", *** v1 debug| [21] = \"h2_rx_window_low_water=64k\", *** v1 debug| [22] = \"-a\", *** v1 debug| [23] = \"127.0.0.1:0\", *** v1 debug| [24] = \"-M\", *** v1 debug| [25] = \"127.0.0.1 61619\", *** v1 debug| [26] = \"-P\", *** v1 debug| [27] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1/vinyld.pid\", *** v1 debug| [28] = \"-p\", *** v1 debug| [29] = \"vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:\", *** v1 debug| [30] = \"-p\", *** v1 debug| [31] = \"feature=+no_coredump\", *** v1 debug| [32] = \"-p\", *** v1 debug| [33] = \"vcc_feature=+allow_inline_c\", *** v1 debug| [34] = \"-p\", *** v1 debug| [35] = \"thread_pool_stack=128k\", *** v1 debug|} *** v1 debug|pthread.self = e *** v1 debug|pthread.name = (cache-worker) *** v1 debug|thr.req = 8345d88 { *** v1 debug| vxid = 1001, transport = HTTP/1 { *** v1 debug| state = HTTP1::Proc *** v1 debug| } *** v1 debug| step = Req Step recv *** v1 debug| req_body = none, *** v1 debug| restarts = 0, esi_level = 0, *** v1 debug| vary_b = 0, vary_e = 0, *** v1 debug| d_ttl = -1.000000, d_grace = -1.000000, *** v1 debug| storage = 0, *** v1 debug| *** v1 debug| director_hint = 8303278 { *** v1 debug| cli_name = vcl1.s1, *** v1 debug| admin_health = healthy, changed = 1773745222.787708, *** v1 debug| type = backend { *** v1 debug| conn_pool = 8345568 { *** v1 debug| ident = 0x158148e252bf4b1f65a78a11df33e182b20ba7abec5105c6bf160d41464722fd, *** v1 debug| vrt_endpoint = 83455d0 { *** v1 debug| ipv4 = 127.0.0.1, port = 59512, *** v1 debug| }, *** v1 debug| }, *** v1 debug| hosthdr = 127.0.0.1, *** v1 debug| n_conn = 0, *** v1 debug| }, *** v1 debug| }, *** v1 debug| sess = 8345a80 { *** v1 debug| fd = 16, vxid = 1000, *** v1 debug| t_open = 1773745222.889841, *** v1 debug| t_idle = 1773745222.889841, *** v1 debug| ws = 8345ab4 { *** v1 debug| id = \"ses\", *** v1 debug| {s, f, r, e} = {8345afc, +96, 0, +616}, *** v1 debug| }, *** v1 debug| transport = HTTP/1 { *** v1 debug| state = HTTP1::Proc *** v1 debug| } *** v1 debug| client = 127.0.0.1 59685 127.0.0.1:38555, *** v1 debug| local.endpoint = 127.0.0.1:38555, *** v1 debug| local.socket = a0, *** v1 debug| local.ip = 127.0.0.1:38555, *** v1 debug| remote.ip = 127.0.0.1:59685, *** v1 debug| server.ip = 127.0.0.1:38555, *** v1 debug| client.ip = 127.0.0.1:59685, *** v1 debug| }, *** v1 debug| worker = fe079d30 { *** v1 debug| ws = fe079d70 { *** v1 debug| id = \"wrk\", *** v1 debug| {s, f, r, e} = {fe0794e0, +0, 0, +2044}, *** v1 debug| }, *** v1 debug| VCL::me *** v1 debug|thod = inside RECV, *** v1 debug| VCL::methods = {RECV}, *** v1 debug| }, *** v1 debug| ws = 8345e68 { *** v1 debug| id = \"req\", *** v1 debug| {s, f, r, e} = {83476c0, +112, 0, +18092}, *** v1 debug| }, *** v1 debug| http_conn = 8347674 { *** v1 debug| fd = 16 (@8345aa0), *** v1 debug| doclose = null(Not Closing) *** v1 debug| ws = 8345e68 { *** v1 debug| [Already dumped, see above] *** v1 debug| }, *** v1 debug| {rxbuf_b, rxbuf_e} = {83476c0, 83476f3}, *** v1 debug| {pipeline_b, pipeline_e} = {0, 0}, *** v1 debug| content_length = -1, *** v1 debug| body_status = none, *** v1 debug| first_byte_timeout = 0.000000, *** v1 debug| between_bytes_timeout = 0.000000, *** v1 debug| }, *** v1 debug| http[req] = 8345edc { *** v1 debug| ws = 8345e68 { *** v1 debug| [Already dumped, see above] *** v1 debug| }, *** v1 debug| hdrs { *** v1 debug| \"GET\", *** v1 debug| \"/\", *** v1 debug| \"HTTP/1.1\", *** v1 debug| \"Host: 127.0.0.1\", *** v1 debug| \"User-Agent: c1\", *** v1 debug| \"X-Forwarded-For: 127.0.0.1\", *** v1 debug| \"Via: 1.1 v1 (Vinyl-Cache/trunk)\", *** v1 debug| }, *** v1 debug| }, *** v1 debug| vdc = 834763c { *** v1 debug| .magic = 0x00000000 EXPECTED: VDP_CTX_MAGIC=0xee501df7 *** v1 debug| } *** v1 debug| vcl[vcl] = 83452b8 { *** v1 debug| name = \"vcl1\", *** v1 debug| busy = 1, *** v1 debug| discard = 0, *** v1 debug| state = auto, *** v1 debug| temp = warm, *** v1 debug| conf = fd1fa520 { *** v1 debug| syntax = \"41\", *** v1 debug| sr *** v1 debug|cname = { *** v1 debug| [0] = \"\", *** v1 debug| [1] = \"\", *** v1 debug| }, *** v1 debug| instances = { *** v1 debug| }, *** v1 debug| }, *** v1 debug| }, *** v1 debug| vpi = fe0794d0 { *** v1 debug| handling (VCL::return) = 0x0 (none), *** v1 debug| ref = 0, *** v1 debug| vpi_ref = fd1fabc0 { *** v1 debug| .magic = 0x00000000 EXPECTED: VPI_REF_MAGIC=0xd955f567 *** v1 debug| } *** v1 debug| }, *** v1 debug| flags = { *** v1 debug| }, *** v1 debug| privs = 8345ed4 { *** v1 debug| }, *** v1 debug| top = 83476b0 { *** v1 debug| req = 8345d88 { *** v1 debug| [Already dumped, see above] *** v1 debug| }, *** v1 debug| privs = 83476bc { *** v1 debug| }, *** v1 debug| vcl[vcl0] = NULL *** v1 debug| }, *** v1 debug|}, *** v1 debug|thr.busyobj = NULL *** v1 debug|thr.worker = fe079d30 { *** v1 debug| [Already dumped, see above] *** v1 debug|}, *** v1 debug|vmods = { *** v1 debug|}, *** v1 debug|pools = { *** v1 debug| pool = 827ef68 { *** v1 debug| nidle = 8, *** v1 debug| nthr = 10, *** v1 debug| lqueue = 0 *** v1 debug| }, *** v1 debug| pool = 82bf8d0 { *** v1 debug| nidle = 9, *** v1 debug| nthr = 10, *** v1 debug| lqueue = 0 *** v1 debug| }, *** v1 debug|}, *** v1 debug| *** v1 debug| *** v1 debug|Debug: Child cleanup complete **** dT 4.341 ** top === vinyl v1 -cliexpect "STACK OVERFLOW" "panic.show" **** dT 4.342 **** v1 CLI TX|panic.show *** v1 CLI RX 200 **** v1 CLI RX|Child (406345) Panic at: Tue, 17 Mar 2026 11:00:22 GMT **** v1 CLI RX|Wrong turn at ../../../../bin/vinyld/cache/cache_main.c:343: **** v1 CLI RX|Signal 11 (Segmentation Fault) received at fe05919c si_code 1 **** v1 CLI RX|THIS PROBABLY IS A STACK OVERFLOW - check thread_pool_stack parameter **** v1 CLI RX|version = vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4, vrt api = 23.0 **** v1 CLI RX|ident = -jsolaris,-sdefault,-sdefault,-hcritbit,ports **** v1 CLI RX|now = 5957299.910516 (mono), 1773745222.890379 (real) **** v1 CLI RX|Backtrace: **** v1 CLI RX| 8149fb3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vbt_execinfo+0x39 [0x8149fb3] **** v1 CLI RX| 814a1c4: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VBT_format+0x2d [0x814a1c4] **** v1 CLI RX| 80aecdd: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_backtrace+0x34 [0x80aecdd] **** v1 CLI RX| 80af020: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_ic+0x27c [0x80af020] **** v1 CLI RX| 81495b9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VAS_Fail+0x3a [0x81495b9] **** v1 CLI RX| 80a8694: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'child_sigmagic+0x0 [0x80a8694] **** v1 CLI RX| fedfad15: /lib/libc.so.1'__sighndlr+0x15 [0xfedfad15] **** v1 CLI RX| fedee8d1: /lib/libc.so.1'call_user_handler+0x1e7 [0xfedee8d1] **** v1 CLI RX| fedeeaf9: /lib/libc.so.1'sigacthandler+0xfd [0xfedeeaf9] **** v1 CLI RX| ffffffff: [0xffffffff] **** v1 CLI RX| 80d6cec: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vcl_call_method+0x422 [0x80d6cec] **** v1 CLI RX| 80d80d3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCL_recv_method+0x121 [0x80d80d3] **** v1 CLI RX| 80b712b: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cnt_recv+0x3c6 [0x80b712b] **** v1 CLI RX| 80b7f12: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'CNT_Request+0x459 [0x80b7f12] **** v1 CLI RX| 80e622e: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'HTTP1_Session+0x83b [0x80e622e] **** v1 CLI RX| 80e4ea9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'http1_req+0xe9 [0x80e4ea9] **** v1 CLI RX| 80da7cf: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'Pool_Work_Thread+0x589 [0x80da7cf] **** v1 CLI RX| 80d9682: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'WRK_Thread+0x2a2 [0x80d9682] **** v1 CLI RX| 80da910: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pool_thread+0x81 [0x80da910] **** v1 CLI RX| fedfa97f: /lib/libc.so.1'_thrp_setup+0x7f [0xfedfa97f] **** v1 CLI RX|argv = { **** v1 CLI RX| [0] = \"vinyld\", **** v1 CLI RX| [1] = \"-d\", **** v1 CLI RX| [2] = \"-n\", **** v1 CLI RX| [3] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1\", **** v1 CLI RX| [4] = \"-i\", **** v1 CLI RX| [5] = \"v1\", **** v1 CLI RX| [6] = \"-l\", **** v1 CLI RX| [7] = \"2m\", **** v1 CLI RX| [8] = \"-p\", **** v1 CLI RX| [9] = \"auto_restart=off\", **** v1 CLI RX| [10] = \"-p\", **** v1 CLI RX| [11] = \"syslog_cli_traffic=off\", **** v1 CLI RX| [12] = \"-p\", **** v1 CLI RX| [13] = \"thread_pool_min=10\", **** v1 CLI RX| [14] = \"-p\", **** v1 CLI RX| [15] = \"debug=+vtc_mode\", **** v1 CLI RX| [16] = \"-p\", **** v1 CLI RX| [17] = \"vsl_mask=+Debug,+H2RxHdr,+H2RxBody\", **** v1 CLI RX| [18] = \"-p\", **** v1 CLI RX| [19] = \"h2_initial_window_size=1m\", **** v1 CLI RX| [20] = \"-p\", **** v1 CLI RX| [21] = \"h2_rx_window_low_water=64k\", **** v1 CLI RX| [22] = \"-a\", **** v1 CLI RX| [23] = \"127.0.0.1:0\", **** v1 CLI RX| [24] = \"-M\", **** v1 CLI RX| [25] = \"127.0.0.1 61619\", **** v1 CLI RX| [26] = \"-P\", **** v1 CLI RX| [27] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1/vinyld.pid\", **** v1 CLI RX| [28] = \"-p\", **** v1 CLI RX| [29] = \"vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:\", **** v1 CLI RX| [30] = \"-p\", **** v1 CLI RX| [31] = \"feature=+no_coredump\", **** v1 CLI RX| [32] = \"-p\", **** v1 CLI RX| [33] = \"vcc_feature=+allow_inline_c\", **** v1 CLI RX| [34] = \"-p\", **** v1 CLI RX| [35] = \"thread_pool_stack=128k\", **** v1 CLI RX|} **** v1 CLI RX|pthread.self = e **** v1 CLI RX|pthread.name = (cache-worker) **** v1 CLI RX|thr.req = 8345d88 { **** v1 CLI RX| vxid = 1001, transport = HTTP/1 { **** v1 CLI RX| state = HTTP1::Proc **** v1 CLI RX| } **** v1 CLI RX| step = Req Step recv **** v1 CLI RX| req_body = none, **** v1 CLI RX| restarts = 0, esi_level = 0, **** v1 CLI RX| vary_b = 0, vary_e = 0, **** v1 CLI RX| d_ttl = -1.000000, d_grace = -1.000000, **** v1 CLI RX| storage = 0, **** v1 CLI RX| director_hint = 8303278 { **** v1 CLI RX| cli_name = vcl1.s1, **** v1 CLI RX| admin_health = healthy, changed = 1773745222.787708, **** v1 CLI RX| type = backend { **** v1 CLI RX| conn_pool = 8345568 { **** v1 CLI RX| ident = 0x158148e252bf4b1f65a78a11df33e182b20ba7abec5105c6bf160d41464722fd, **** v1 CLI RX| vrt_endpoint = 83455d0 { **** v1 CLI RX| ipv4 = 127.0.0.1, port = 59512, **** v1 CLI RX| }, **** v1 CLI RX| }, **** v1 CLI RX| hosthdr = 127.0.0.1, **** v1 CLI RX| n_conn = 0, **** v1 CLI RX| }, **** v1 CLI RX| }, **** v1 CLI RX| sess = 8345a80 { **** v1 CLI RX| fd = 16, vxid = 1000, **** v1 CLI RX| t_open = 1773745222.889841, **** v1 CLI RX| t_idle = 1773745222.889841, **** v1 CLI RX| ws = 8345ab4 { **** v1 CLI RX| id = \"ses\", **** v1 CLI RX| {s, f, r, e} = {8345afc, +96, 0, +616}, **** v1 CLI RX| }, **** v1 CLI RX| transport = HTTP/1 { **** v1 CLI RX| state = HTTP1::Proc **** v1 CLI RX| } **** v1 CLI RX| client = 127.0.0.1 59685 127.0.0.1:38555, **** v1 CLI RX| local.endpoint = 127.0.0.1:38555, **** v1 CLI RX| local.socket = a0, **** v1 CLI RX| local.ip = 127.0.0.1:38555, **** v1 CLI RX| remote.ip = 127.0.0.1:59685, **** v1 CLI RX| server.ip = 127.0.0.1:38555, **** v1 CLI RX| client.ip = 127.0.0.1:59685, **** v1 CLI RX| }, **** v1 CLI RX| worker = fe079d30 { **** v1 CLI RX| ws = fe079d70 { **** v1 CLI RX| id = \"wrk\", **** v1 CLI RX| {s, f, r, e} = {fe0794e0, +0, 0, +2044}, **** v1 CLI RX| }, **** v1 CLI RX| VCL::method = inside RECV, **** v1 CLI RX| VCL::methods = {RECV}, **** v1 CLI RX| }, **** v1 CLI RX| ws = 8345e68 { **** v1 CLI RX| id = \"req\", **** v1 CLI RX| {s, f, r, e} = {83476c0, +112, 0, +18092}, **** v1 CLI RX| }, **** v1 CLI RX| http_conn = 8347674 { **** v1 CLI RX| fd = 16 (@8345aa0), **** v1 CLI RX| doclose = null(Not Closing) **** v1 CLI RX| ws = 8345e68 { **** v1 CLI RX| [Already dumped, see above] **** v1 CLI RX| }, **** v1 CLI RX| {rxbuf_b, rxbuf_e} = {83476c0, 83476f3}, **** v1 CLI RX| {pipeline_b, pipeline_e} = {0, 0}, **** v1 CLI RX| content_length = -1, **** v1 CLI RX| body_status = none, **** v1 CLI RX| first_byte_timeout = 0.000000, **** v1 CLI RX| between_bytes_timeout = 0.000000, **** v1 CLI RX| }, **** v1 CLI RX| http[req] = 8345edc { **** v1 CLI RX| ws = 8345e68 { **** v1 CLI RX| [Already dumped, see above] **** v1 CLI RX| }, **** v1 CLI RX| hdrs { **** v1 CLI RX| \"GET\", **** v1 CLI RX| \"/\", **** v1 CLI RX| \"HTTP/1.1\", **** v1 CLI RX| \"Host: 127.0.0.1\", **** v1 CLI RX| \"User-Agent: c1\", **** v1 CLI RX| \"X-Forwarded-For: 127.0.0.1\", **** v1 CLI RX| \"Via: 1.1 v1 (Vinyl-Cache/trunk)\", **** v1 CLI RX| }, **** v1 CLI RX| }, **** v1 CLI RX| vdc = 834763c { **** v1 CLI RX| .magic = 0x00000000 EXPECTED: VDP_CTX_MAGIC=0xee501df7 **** v1 CLI RX| } **** v1 CLI RX| vcl[vcl] = 83452b8 { **** v1 CLI RX| name = \"vcl1\", **** v1 CLI RX| busy = 1, **** v1 CLI RX| discard = 0, **** v1 CLI RX| state = auto, **** v1 CLI RX| temp = warm, **** v1 CLI RX| conf = fd1fa520 { **** v1 CLI RX| syntax = \"41\", **** v1 CLI RX| srcname = { **** v1 CLI RX| [0] = \"\", **** v1 CLI RX| [1] = \"\", **** v1 CLI RX| }, **** v1 CLI RX| instances = { **** v1 CLI RX| }, **** v1 CLI RX| }, **** v1 CLI RX| }, **** v1 CLI RX| vpi = fe0794d0 { **** v1 CLI RX| handling (VCL::return) = 0x0 (none), **** v1 CLI RX| ref = 0, **** v1 CLI RX| vpi_ref = fd1fabc0 { **** v1 CLI RX| .magic = 0x00000000 EXPECTED: VPI_REF_MAGIC=0xd955f567 **** v1 CLI RX| } **** v1 CLI RX| }, **** v1 CLI RX| flags = { **** v1 CLI RX| }, **** v1 CLI RX| privs = 8345ed4 { **** v1 CLI RX| }, **** v1 CLI RX| top = 83476b0 { **** v1 CLI RX| req = 8345d88 { **** v1 CLI RX| [Already dumped, see above] **** v1 CLI RX| }, **** v1 CLI RX| privs = 83476bc { **** v1 CLI RX| }, **** v1 CLI RX| vcl[vcl0] = NULL **** v1 CLI RX| }, **** v1 CLI RX|}, **** v1 CLI RX|thr.busyobj = NULL **** v1 CLI RX|thr.worker = fe079d30 { **** v1 CLI RX| [Already dumped, see above] **** v1 CLI RX|}, **** v1 CLI RX|vmods = { **** v1 CLI RX|}, **** v1 CLI RX|pools = { **** v1 CLI RX| pool = 827ef68 { **** v1 CLI RX| nidle = 8, **** v1 CLI RX| nthr = 10, **** v1 CLI RX| lqueue = 0 **** v1 CLI RX| }, **** v1 CLI RX| pool = 82bf8d0 { **** v1 CLI RX| nidle = 9, **** v1 CLI RX| nthr = 10, **** v1 CLI RX| lqueue = 0 **** v1 CLI RX| }, **** v1 CLI RX|}, **** v1 CLI RX| **** v1 CLI RX| ** v1 CLI 200 ** top === vinyl v1 -clijson "panic.show -j" **** v1 CLI TX|panic.show -j **** dT 4.343 *** v1 CLI RX 200 **** v1 CLI RX|[ 2, ["panic.show", "-j"], 1773745225.897, **** v1 CLI RX| "Child (406345) Panic at: Tue, 17 Mar 2026 11:00:22 GMT\nWrong turn at ../../../../bin/vinyld/cache/cache_main.c:343:\nSignal 11 (Segmentation Fault) received at fe05919c si_code 1\nTHIS PROBABLY IS A STACK OVERFLOW - check thread_pool_stack parameter\nversion = vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4, vrt api = 23.0\nident = -jsolaris,-sdefault,-sdefault,-hcritbit,ports\nnow = 5957299.910516 (mono), 1773745222.890379 (real)\nBacktrace:\n 8149fb3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vbt_execinfo+0x39 [0x8149fb3]\n 814a1c4: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VBT_format+0x2d [0x814a1c4]\n 80aecdd: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_backtrace+0x34 [0x80aecdd]\n 80af020: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_ic+0x27c [0x80af020]\n 81495b9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VAS_Fail+0x3a [0x81495b9]\n 80a8694: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'child_sigmagic+0x0 [0x80a8694]\n fedfad15: /lib/libc.so.1'__sighndlr+0x15 [0xfedfad15]\n fedee8d1: /lib/libc.so.1'call_user_handler+0x1e7 [0xfedee8d1]\n fedeeaf9: /lib/libc.so.1'sigacthandler+0xfd [0xfedeeaf9]\n ffffffff: [0xffffffff]\n 80d6cec: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vcl_call_method+0x422 [0x80d6cec]\n 80d80d3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCL_recv_method+0x121 [0x80d80d3]\n 80b712b: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cnt_recv+0x3c6 [0x80b712b]\n 80b7f12: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'CNT_Request+0x459 [0x80b7f12]\n 80e622e: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'HTTP1_Session+0x83b [0x80e622e]\n 80e4ea9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'http1_req+0xe9 [0x80e4ea9]\n 80da7cf: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'Pool_Work_Thread+0x589 [0x80da7cf]\n 80d9682: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'WRK_Thread+0x2a2 [0x80d9682]\n 80da910: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pool_thread+0x81 [0x80da910]\n fedfa97f: /lib/libc.so.1'_thrp_setup+0x7f [0xfedfa97f]\nargv = {\n [0] = \\\"vinyld\\\",\n [1] = \\\"-d\\\",\n [2] = \\\"-n\\\",\n [3] = \\\"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1\\\",\n [4] = \\\"-i\\\",\n [5] = \\\"v1\\\",\n [6] = \\\"-l\\\",\n [7] = \\\"2m\\\",\n [8] = \\\"-p\\\",\n [9] = \\\"auto_restart=off\\\",\n [10] = \\\"-p\\\",\n [11] = \\\"syslog_cli_traffic=off\\\",\n [12] = \\\"-p\\\",\n [13] = \\\"thread_pool_min=10\\\",\n [14] = \\\"-p\\\",\n [15] = \\\"debug=+vtc_mode\\\",\n [16] = \\\"-p\\\",\n [17] = \\\"vsl_mask=+Debug,+H2RxHdr,+H2RxBody\\\",\n [18] = \\\"-p\\\",\n [19] = \\\"h2_initial_window_size=1m\\\",\n [20] = \\\"-p\\\",\n [21] = \\\"h2_rx_window_low_water=64k\\\",\n [22] = \\\"-a\\\",\n [23] = \\\"127.0.0.1:0\\\",\n [24] = \\\"-M\\\",\n [25] = \\\"127.0.0.1 61619\\\",\n [26] = \\\"-P\\\",\n [27] = \\\"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v1/vinyld.pid\\\",\n [28] = \\\"-p\\\",\n [29] = \\\"vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:\\\",\n [30] = \\\"-p\\\",\n [31] = \\\"feature=+no_coredump\\\",\n [32] = \\\"-p\\\",\n [33] = \\\"vcc_feature=+allow_inline_c\\\",\n [34] = \\\"-p\\\",\n [35] = \\\"thread_pool_stack=128k\\\",\n}\npthread.self = e\npthread.name = (cache-worker)\nthr.req = 8345d88 {\n vxid = 1001, transport = HTTP/1 {\n state = HTTP1::Proc\n }\n step = Req Step recv\n req_body = none,\n restarts = 0, esi_level = 0,\n vary_b = 0, vary_e = 0,\n d_ttl = -1.000000, d_grace = -1.000000,\n storage = 0,\n director_hint = 8303278 {\n cli_name = vcl1.s1,\n admin_health = healthy, changed = 1773745222.787708,\n type = backend {\n conn_pool = 8345568 {\n ident = 0x158148e252bf4b1f65a78a11df33e182b20ba7abec5105c6bf160d41464722fd,\n vrt_endpoint = 83455d0 {\n ipv4 = 127.0.0.1, port = 59512,\n },\n },\n hosthdr = 127.0.0.1,\n n_conn = 0,\n },\n },\n sess = 8345a80 {\n fd = 16, vxid = 1000,\n t_open = 1773745222.889841,\n t_idle = 1773745222.889841,\n ws = 8345ab4 {\n id = \\\"ses\\\",\n {s, f, r, e} = {8345afc, +96, 0, +616},\n },\n transport = HTTP/1 {\n state = HTTP1::Proc\n }\n client = 127.0.0.1 59685 127.0.0.1:38555,\n local.endpoint = 127.0.0.1:38555,\n local.socket = a0,\n local.ip = 127.0.0.1:38555,\n remote.ip = 127.0.0.1:59685,\n server.ip = 127.0.0.1:38555,\n client.ip = 127.0.0.1:59685,\n },\n worker = fe079d30 {\n ws = fe079d70 {\n id = \\\"wrk\\\",\n {s, f, r, e} = {fe0794e0, +0, 0, +2044},\n },\n VCL::method = inside RECV,\n VCL::methods = {RECV},\n },\n ws = 8345e68 {\n id = \\\"req\\\",\n {s, f, r, e} = {83476c0, +112, 0, +18092},\n },\n http_conn = 8347674 {\n fd = 16 (@8345aa0),\n doclose = null(Not Closing)\n ws = 8345e68 {\n [Already dumped, see above]\n },\n {rxbuf_b, rxbuf_e} = {83476c0, 83476f3},\n {pipeline_b, pipeline_e} = {0, 0},\n content_length = -1,\n body_status = none,\n first_byte_timeout = 0.000000,\n between_bytes_timeout = 0.000000,\n },\n http[req] = 8345edc {\n ws = 8345e68 {\n [Already dumped, see above]\n },\n hdrs {\n \\\"GET\\\",\n \\\"/\\\",\n \\\"HTTP/1.1\\\",\n \\\"Host: 127.0.0.1\\\",\n \\\"User-Agent: c1\\\",\n \\\"X-Forwarded-For: 127.0.0.1\\\",\n \\\"Via: 1.1 v1 (Vinyl-Cache/trunk)\\\",\n },\n },\n vdc = 834763c {\n .magic = 0x00000000 EXPECTED: VDP_CTX_MAGIC=0xee501df7\n }\n vcl[vcl] = 83452b8 {\n name = \\\"vcl1\\\",\n busy = 1,\n discard = 0,\n state = auto,\n temp = warm,\n conf = fd1fa520 {\n syntax = \\\"41\\\",\n srcname = {\n [0] = \\\"\\\",\n [1] = \\\"\\\",\n },\n instances = {\n },\n },\n },\n vpi = fe0794d0 {\n handling (VCL::return) = 0x0 (none),\n ref = 0,\n vpi_ref = fd1fabc0 {\n .magic = 0x00000000 EXPECTED: VPI_REF_MAGIC=0xd955f567\n }\n },\n flags = {\n },\n privs = 8345ed4 {\n },\n top = 83476b0 {\n req = 8345d88 {\n [Already dumped, see above]\n },\n privs = 83476bc {\n },\n vcl[vcl0] = NULL\n },\n},\nthr.busyobj = NULL\nthr.worker = fe079d30 {\n [Already dumped, see above]\n},\nvmods = {\n},\npools = {\n pool = 827ef68 {\n nidle = 8,\n nthr = 10,\n lqueue = 0\n },\n pool = 82bf8d0 {\n nidle = 9,\n nthr = 10,\n lqueue = 0\n },\n},\n\n" **** v1 CLI RX|] ** v1 CLI 200 ** top === vinyl v1 -cliok "panic.clear" **** v1 CLI TX|panic.clear *** v1 CLI RX 200 ** v1 CLI 200 ** top === vinyl v1 -cliok "param.set sigsegv_handler off" **** v1 CLI TX|param.set sigsegv_handler off *** v1 CLI RX 200 ** v1 CLI 200 ** top === vinyl v1 -vcl+backend {} -start **** v1 CLI TX|vcl.inline vcl2 << %XJEIFLH|)Xspa8P **** v1 CLI TX|vcl 4.1; **** v1 CLI TX|backend s1 { .host = "127.0.0.1"; .port = "59512"; } **** v1 CLI TX| **** v1 CLI TX| **** v1 CLI TX|%XJEIFLH|)Xspa8P **** dT 5.238 *** v1 CLI RX 200 **** v1 CLI RX|Message from VCC-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|Message from C-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|Message from dlopen: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|VCL compiled. **** v1 CLI TX|vcl.use vcl2 *** v1 CLI RX 200 **** v1 CLI RX|VCL 'vcl2' now active ** v1 Start **** v1 CLI TX|start **** dT 5.253 *** v1 debug|Debug: *** v1 debug| Child (408479) Started **** dT 5.292 *** v1 debug|Child launched OK **** dT 5.295 *** v1 CLI RX 200 *** v1 wait-running **** v1 CLI TX|status *** v1 debug|Info: *** v1 debug| *** v1 debug|Child (408479) said Child starts *** v1 debug| *** v1 debug|Info: *** v1 debug| *** v1 debug|Child (408479) said Security: proc_setid missing, uid/gid unchanged *** v1 debug| **** dT 5.296 *** v1 CLI RX 200 **** v1 CLI RX|Child in state running **** v1 CLI TX|debug.listen_address *** v1 CLI RX 200 **** v1 CLI RX|a0 127.0.0.1 38555 **** v1 CLI TX|debug.xid 1000 *** v1 CLI RX 200 **** v1 CLI RX|XID is 1000 chunk 1 **** v1 CLI TX|debug.listen_address *** v1 CLI RX 200 **** v1 CLI RX|a0 127.0.0.1 38555 ** v1 Listen on 127.0.0.1 38555 **** v1 macro def v1_addr=127.0.0.1 **** v1 macro def v1_port=38555 **** v1 macro def v1_sock=127.0.0.1:38555 **** v1 macro def v1_a0_addr=127.0.0.1 **** v1 macro def v1_a0_port=38555 **** v1 macro def v1_a0_sock=127.0.0.1:38555 ** top === client c1 { ** c1 Starting client ** c1 Waiting for client ** c1 Started on 127.0.0.1:38555 (1 iterations) *** c1 Connect to 127.0.0.1:38555 *** c1 connected fd 16 from 127.0.0.1 40755 to 127.0.0.1:38555 ** c1 === txreq **** c1 txreq|GET / HTTP/1.1\r **** c1 txreq|Host: 127.0.0.1\r **** c1 txreq|User-Agent: c1\r **** c1 txreq|\r ** c1 === rxresp **** dT 5.377 *** s1 accepted fd 4 127.0.0.1 38387 ** s1 === rxreq **** dT 5.378 **** s1 rxhdr|GET / HTTP/1.1\r **** s1 rxhdr|Host: 127.0.0.1\r **** s1 rxhdr|User-Agent: c1\r **** s1 rxhdr|X-Forwarded-For: 127.0.0.1\r **** s1 rxhdr|Via: 1.1 v1 (Vinyl-Cache/trunk)\r **** s1 rxhdr|Accept-Encoding: gzip\r **** s1 rxhdr|X-Vinyl: 1002\r **** s1 rxhdr|\r **** s1 rxhdrlen = 150 **** s1 http[ 0] |GET **** s1 http[ 1] |/ **** s1 http[ 2] |HTTP/1.1 **** s1 http[ 3] |Host: 127.0.0.1 **** s1 http[ 4] |User-Agent: c1 **** s1 http[ 5] |X-Forwarded-For: 127.0.0.1 **** s1 http[ 6] |Via: 1.1 v1 (Vinyl-Cache/trunk) **** s1 http[ 7] |Accept-Encoding: gzip **** s1 http[ 8] |X-Vinyl: 1002 **** s1 bodylen = 0 ** s1 === txresp **** s1 txresp|HTTP/1.1 200 OK\r **** s1 txresp|Date: Tue, 17 Mar 2026 11:00:26 GMT\r **** s1 txresp|Server: s1\r **** s1 txresp|Content-Length: 0\r **** s1 txresp|\r *** s1 shutting fd 4 (server run) ** s1 Ending **** dT 5.380 **** v1 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1773745221.726507/vgc.so 1auto **** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1773745221.726507/vgc.so" as "vcl1" **** v1 vsl| 0 CLI - Rd vcl.load "vcl2" vcl_vcl2.1773745225.898075/vgc.so 1auto **** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl2.1773745225.898075/vgc.so" as "vcl2" **** v1 vsl| 0 CLI - Rd vcl.use "vcl2" **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd start **** v1 vsl| 0 Debug - sockopt: Setting SO_LINGER for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPIDLE for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPCNT for a0=127.0.0.1:38555 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPINTVL for a0=127.0.0.1:38555 **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 38555 **** v1 vsl| 0 CLI - Rd debug.xid 1000 **** v1 vsl| 0 CLI - Wr 200 19 XID is 1000 chunk 1 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 38555 **** v1 vsl| 1000 Begin c sess 0 HTTP/1 **** v1 vsl| 1000 SessOpen c 127.0.0.1 40755 a0 127.0.0.1 38555 1773745226.930900 16 **** v1 vsl| 1000 Debug c sockopt: Test confirmed SO_KEEPALIVE non heredity for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: SO_LINGER may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: SO_SNDTIMEO may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: SO_RCVTIMEO may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_NODELAY may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_KEEPIDLE may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_KEEPCNT may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Debug c sockopt: TCP_KEEPINTVL may be inherited for a0=127.0.0.1:38555 **** v1 vsl| 1000 Link c req 1001 rxreq **** dT 5.389 **** c1 rxhdr|HTTP/1.1 200 OK\r **** c1 rxhdr|Date: Tue, 17 Mar 2026 11:00:26 GMT\r **** c1 rxhdr|Server: s1\r **** c1 rxhdr|Content-Length: 0\r **** c1 rxhdr|X-Vinyl: 1001\r **** c1 rxhdr|Age: 0\r **** c1 rxhdr|Via: 1.1 v1 (Vinyl-Cache/trunk)\r **** c1 rxhdr|Accept-Ranges: bytes\r **** c1 rxhdr|Connection: keep-alive\r **** c1 rxhdr|\r **** c1 rxhdrlen = 189 **** c1 http[ 0] |HTTP/1.1 **** c1 http[ 1] |200 **** c1 http[ 2] |OK **** c1 http[ 3] |Date: Tue, 17 Mar 2026 11:00:26 GMT **** c1 http[ 4] |Server: s1 **** c1 http[ 5] |Content-Length: 0 **** c1 http[ 6] |X-Vinyl: 1001 **** c1 http[ 7] |Age: 0 **** c1 http[ 8] |Via: 1.1 v1 (Vinyl-Cache/trunk) **** c1 http[ 9] |Accept-Ranges: bytes **** c1 http[10] |Connection: keep-alive **** c1 bodylen = 0 *** c1 closing fd 16 **** dT 5.390 ** c1 Ending ** top === vinyl v1 -expectexit 0x40 ** top === vinyl v2 \ **** dT 5.402 ** v2 Launch *** v2 CMD: cd ${pwd} && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2 -i v2 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 54624' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: -p feature=+no_coredump -p vcc_feature=+allow_inline_c *** v2 CMD: cd /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2 -i v2 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 54624' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: -p feature=+no_coredump -p vcc_feature=+allow_inline_c **** dT 5.403 *** v2 PID: 408607 **** v2 macro def v2_pid=408607 **** v2 macro def v2_name=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2 **** dT 5.452 *** v2 debug|Warning: mlock() of VSM failed: Not owner (1) **** dT 5.457 *** v2 debug|Debug: Version: vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v2 debug| *** v2 debug|Debug: Platform: -jsolaris,-sdefault,-sdefault,-hcritbit *** v2 debug|200 292 *** v2 debug|----------------------------- *** v2 debug|Vinyl Cache CLI 1.0 *** v2 debug|----------------------------- *** v2 debug|-jsolaris,-sdefault,-sdefault,-hcritbit *** v2 debug|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v2 debug| *** v2 debug|Type 'help' for command list. *** v2 debug|Type 'quit' to close CLI session. *** v2 debug|Type 'start' to launch worker process. *** v2 debug| **** dT 5.480 **** v1 vsl| 1002 Begin b bereq 1001 fetch **** v1 vsl| 1002 VCL_use b vcl2 **** v1 vsl| 1002 Timestamp b Start: 1773745226.931686 0.000000 0.000000 **** v1 vsl| 1002 BereqMethod b GET **** v1 vsl| 1002 BereqURL b / **** v1 vsl| 1002 BereqProtocol b HTTP/1.1 **** v1 vsl| 1002 BereqHeader b Host: 127.0.0.1 **** v1 vsl| 1002 BereqHeader b User-Agent: c1 **** v1 vsl| 1002 BereqHeader b X-Forwarded-For: 127.0.0.1 **** v1 vsl| 1002 BereqHeader b Via: 1.1 v1 (Vinyl-Cache/trunk) **** v1 vsl| 1002 BereqHeader b Accept-Encoding: gzip **** v1 vsl| 1002 BereqHeader b X-Vinyl: 1002 **** v1 vsl| 1002 VCL_call b BACKEND_FETCH **** v1 vsl| 1002 VCL_return b fetch **** v1 vsl| 1002 Timestamp b Fetch: 1773745226.931770 0.000084 0.000084 **** v1 vsl| 1002 Timestamp b Connected: 1773745226.931956 0.000270 0.000185 **** v1 vsl| 1002 BackendOpen b 18 s1 127.0.0.1 59512 127.0.0.1 38387 connect **** v1 vsl| 1002 Timestamp b Bereq: 1773745226.932043 0.000357 0.000087 **** v1 vsl| 1002 BerespProtocol b HTTP/1.1 **** v1 vsl| 1002 BerespStatus b 200 **** v1 vsl| 1002 BerespReason b OK **** v1 vsl| 1002 BerespHeader b Date: Tue, 17 Mar 2026 11:00:26 GMT **** v1 vsl| 1002 BerespHeader b Server: s1 **** v1 vsl| 1002 BerespHeader b Content-Length: 0 **** v1 vsl| 1002 Timestamp b Beresp: 1773745226.932885 0.001199 0.000841 **** v1 vsl| 1002 TTL b RFC 120 10 0 1773745227 1773745227 1773745226 0 0 cacheable **** v1 vsl| 1002 VCL_call b BACKEND_RESPONSE **** v1 vsl| 1002 VCL_return b deliver **** v1 vsl| 1002 Debug b Missing content-range header or unknown range unit **** v1 vsl| 1002 Timestamp b Process: 1773745226.932989 0.001303 0.000104 **** v1 vsl| 1002 Filters b **** v1 vsl| 1002 Storage b umem s0 **** v1 vsl| 1002 Fetch_Body b 0 none - **** v1 vsl| 1002 BackendClose b 18 s1 recycle **** v1 vsl| 1002 Timestamp b BerespBody: 1773745226.943384 0.011698 0.010394 **** v1 vsl| 1002 Length b 0 **** v1 vsl| 1002 BereqAcct b 150 0 150 87 0 87 **** v1 vsl| 1002 End b **** v1 vsl| 1001 Begin c req 1000 rxreq **** v1 vsl| 1001 Timestamp c Start: 1773745226.931257 0.000000 0.000000 **** v1 vsl| 1001 Timestamp c Req: 1773745226.931257 0.000000 0.000000 **** v1 vsl| 1001 VCL_use c vcl2 **** v1 vsl| 1001 ReqStart c 127.0.0.1 40755 a0 **** v1 vsl| 1001 ReqMethod c GET **** v1 vsl| 1001 ReqURL c / **** v1 vsl| 1001 ReqProtocol c HTTP/1.1 **** v1 vsl| 1001 ReqHeader c Host: 127.0.0.1 **** v1 vsl| 1001 ReqHeader c User-Agent: c1 **** v1 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1 **** v1 vsl| 1001 ReqHeader c Via: 1.1 v1 (Vinyl-Cache/trunk) **** v1 vsl| 1001 VCL_call c RECV **** v1 vsl| 1001 VCL_return c hash **** v1 vsl| 1001 VCL_call c HASH **** v1 vsl| 1001 VCL_return c lookup **** v1 vsl| 1001 VCL_call c MISS **** v1 vsl| 1001 VCL_return c fetch **** v1 vsl| 1001 Link c bereq 1002 fetch **** v1 vsl| 1001 Timestamp c Fetch: 1773745226.943401 0.012144 0.012144 **** v1 vsl| 1001 RespProtocol c HTTP/1.1 **** v1 vsl| 1001 RespStatus c 200 **** v1 vsl| 1001 RespReason c OK **** v1 vsl| 1001 RespHeader c Date: Tue, 17 Mar 2026 11:00:26 GMT **** v1 vsl| 1001 RespHeader c Server: s1 **** v1 vsl| 1001 RespHeader c Content-Length: 0 **** v1 vsl| 1001 RespHeader c X-Vinyl: 1001 **** v1 vsl| 1001 RespHeader c Age: 0 **** v1 vsl| 1001 RespHeader c Via: 1.1 v1 (Vinyl-Cache/trunk) **** v1 vsl| 1001 RespHeader c Accept-Ranges: bytes **** v1 vsl| 1001 VCL_call c DELIVER **** v1 vsl| 1001 VCL_return c deliver **** v1 vsl| 1001 Timestamp c Process: 1773745226.943475 0.012217 0.000073 **** v1 vsl| 1001 Filters c **** v1 vsl| 1001 RespHeader c Connection: keep-alive **** v1 vsl| 1001 Timestamp c Resp: 1773745226.943516 0.012259 0.000041 **** v1 vsl| 1001 ReqAcct c 51 0 51 189 0 189 **** v1 vsl| 1001 End c **** v1 vsl| 1000 SessClose c REM_CLOSE 0.013 **** v1 vsl| 1000 End c **** dT 5.554 **** v2 CLIPOLL 1 0x1 0x0 0x0 *** v2 CLI connection fd = 16 *** v2 CLI RX 107 **** v2 CLI RX|qbebmrmmpxdxmifopqsuurphmwbbyxnz **** v2 CLI RX| **** v2 CLI RX|Authentication required. **** dT 5.555 **** v2 CLI TX|auth c59bbc66f62434ab1d3781b06f9e811a83cb2770c6068f0f8ea95df67b6055bc **** dT 5.556 *** v2 CLI RX 200 **** v2 CLI RX|----------------------------- **** v2 CLI RX|Vinyl Cache CLI 1.0 **** v2 CLI RX|----------------------------- **** v2 CLI RX|-jsolaris,-sdefault,-sdefault,-hcritbit **** v2 CLI RX|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 **** v2 CLI RX| **** v2 CLI RX|Type 'help' for command list. **** v2 CLI RX|Type 'quit' to close CLI session. **** v2 CLI RX|Type 'start' to launch worker process. **** v2 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P **** v2 CLI TX|vcl 4.1; **** v2 CLI TX|backend s1 { .host = "127.0.0.1"; .port = "59512"; } **** v2 CLI TX| **** v2 CLI TX| **** v2 CLI TX| **** v2 CLI TX|\tC{ **** v2 CLI TX|\t#include **** v2 CLI TX|\t}C **** v2 CLI TX| **** v2 CLI TX|\tsub vcl_recv { C{ **** v2 CLI TX|\t int *i = (void *)VRT_GetHdr; **** v2 CLI TX|\t *i = 42; **** v2 CLI TX|\t}C } **** v2 CLI TX| **** v2 CLI TX|%XJEIFLH|)Xspa8P **** dT 5.656 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 5.756 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 5.856 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 5.956 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 6.056 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 6.156 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 6.257 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 6.357 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 6.452 *** v2 CLI RX 200 **** v2 CLI RX|Message from VCC-compiler: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|Message from C-compiler: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|Message from dlopen: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|VCL compiled. **** v2 CLI TX|vcl.use vcl1 *** v2 CLI RX 200 **** v2 CLI RX|VCL 'vcl1' now active ** v2 Start **** v2 CLI TX|start **** dT 6.457 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 6.471 *** v2 debug|Debug: *** v2 debug| Child (409164) Started **** dT 6.493 *** v2 debug|Error: Child failed on launch *** v2 debug|Error: Child (409164) said Child starts *** v2 debug|Error: Child (409164) said Security: proc_setid missing, uid/gid unchanged **** dT 6.593 *** v2 debug|Error: Child (409164) died signal=6 *** v2 debug|Error: *** v2 debug|Child (409164) Panic at: Tue, 17 Mar 2026 11:00:28 GMT *** v2 debug|Wrong turn at ../../../../bin/vinyld/cache/cache_mempool.c:246: *** v2 debug|pthread_create(&mpl->thread, ((void *)0), mpl_guard, mpl) failed *** v2 debug|version = vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4, vrt api = 23.0 *** v2 debug|ident = -jsolaris,-sdefault,-sdefault,-hcritbit,ports *** v2 debug|now = 5957305.066380 (mono), 1773745228.046132 (real) *** v2 debug|Backtrace: *** v2 debug| 8149fb3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vbt_execinfo+0x39 [0x8149fb3] *** v2 debug| 814a1c4: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VBT_format+0x2d [0x814a1c4] *** v2 debug| 80aecdd: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_backtrace+0x34 [0x80aecdd] *** v2 debug| 80af020: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_ic+0x27c [0x80af020] *** v2 debug| 81495b9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld **** dT 6.594 *** v2 debug|/vinyld'VAS_Fail+0x3a [0x81495b9] *** v2 debug| 80a9ae9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'MPL_New+0x182 [0x80a9ae9] *** v2 debug| 80bb63d: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'SES_NewPool+0x13c [0x80bb63d] *** v2 debug| 80afa47: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pool_mkpool+0x21a [0x80afa47] *** v2 debug| 80afa9e: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pool_poolherder+0x41 [0x80afa9e] *** v2 debug| fedfa97f: /lib/libc.so.1'_thrp_setup+0x7f [0xfedfa97f] *** v2 debug| fedfac30: /lib/libc.so.1'_lwp_start+0x0 [0xfedfac30] *** v2 debug|errno = 11 (Resource temporarily unavailable) *** v2 debug|argv = { *** v2 debug| [0] = \"vinyld\", *** v2 debug| [1] = \"-d\", *** v2 debug| [2] = \"-n\", *** v2 debug| [3] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2\", *** v2 debug| [4] = \"-i\", *** v2 debug| [5] = \"v2\", *** v2 debug| [6] = \"-l\", *** v2 debug| [7] = \"2m\", *** v2 debug| [8] = \"-p\", *** v2 debug| [9] = \"auto_restart=off\", *** v2 debug| [10] = \"-p\", *** v2 debug| [11] = \"syslog_cli_traffic *** v2 debug|=off\", *** v2 debug| [12] = \"-p\", *** v2 debug| [13] = \"thread_pool_min=10\", *** v2 debug| [14] = \"-p\", *** v2 debug| [15] = \"debug=+vtc_mode\", *** v2 debug| [16] = \"-p\", *** v2 debug| [17] = \"vsl_mask=+Debug,+H2RxHdr,+H2RxBody\", *** v2 debug| [18] = \"-p\", *** v2 debug| [19] = \"h2_initial_window_size=1m\", *** v2 debug| [20] = \"-p\", *** v2 debug| [21] = \"h2_rx_window_low_water=64k\", *** v2 debug| [22] = \"-a\", *** v2 debug| [23] = \"127.0.0.1:0\", *** v2 debug| [24] = \"-M\", *** v2 debug| [25] = \"127.0.0.1 54624\", *** v2 debug| [26] = \"-P\", *** v2 debug| [27] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2/vinyld.pid\", *** v2 debug| [28] = \"-p\", *** v2 debug| [29] = \"vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:\", *** v2 debug| [30] = \"-p\", *** v2 debug| [31] = \"feature=+no_coredump\", *** v2 debug| [32] = \"-p\", *** v2 debug| [33] = \"vcc_feature=+allow_inline_c\", *** v2 debug|} *** v2 debug|pthread.self = 4 *** v2 debug|pthread.name = (pool_poolherder) *** v2 debug|thr.req = NULL *** v2 debug|thr.busyobj = NULL *** v2 debug|thr.worker = NULL *** v2 debug|vmods = { *** v2 debug|}, *** v2 debug|pools = { *** v2 debug|}, *** v2 debug| *** v2 debug| *** v2 debug|Debug: *** v2 debug|Child cleanup complete *** v2 CLI RX 400 **** v2 CLI RX|Child failed on launch **** dT 6.604 ---- v2 CLI start command failed: 400 Child failed on launch * top RESETTING after ../../../../bin/vinyltest/tests/c00057.vtc ** s1 Waiting for server (3/-1) ** v1 Wait **** v1 CLI TX|panic.show *** v1 CLI RX 300 **** v1 CLI RX|Child has not panicked or panic has been cleared *** v1 debug|Info: manager stopping child *** v1 debug|Debug: Stopping Child **** dT 6.681 **** v1 vsl| 0 CLI - EOF on CLI connection, worker stops **** dT 6.704 *** v1 debug|Info: Child (408479) said Child dies *** v1 debug|Info: Child (408479) ended *** v1 debug|Debug: Child cleanup complete *** v1 debug| *** v1 debug|Info: manager dies **** dT 6.705 **** v1 STDOUT EOF **** dT 6.781 ** v1 WAIT4 pid=405331 status=0x4000 (user 1.661000 sys 0.318000) **** dT 6.782 ** v2 Wait **** v2 CLI TX|panic.show *** v2 CLI RX 200 **** v2 CLI RX|Child (409164) Panic at: Tue, 17 Mar 2026 11:00:28 GMT **** v2 CLI RX|Wrong turn at ../../../../bin/vinyld/cache/cache_mempool.c:246: **** v2 CLI RX|pthread_create(&mpl->thread, ((void *)0), mpl_guard, mpl) failed **** v2 CLI RX|version = vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4, vrt api = 23.0 **** v2 CLI RX|ident = -jsolaris,-sdefault,-sdefault,-hcritbit,ports **** v2 CLI RX|now = 5957305.066380 (mono), 1773745228.046132 (real) **** v2 CLI RX|Backtrace: **** v2 CLI RX| 8149fb3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vbt_execinfo+0x39 [0x8149fb3] **** v2 CLI RX| 814a1c4: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VBT_format+0x2d [0x814a1c4] **** v2 CLI RX| 80aecdd: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_backtrace+0x34 [0x80aecdd] **** v2 CLI RX| 80af020: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_ic+0x27c [0x80af020] **** v2 CLI RX| 81495b9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VAS_Fail+0x3a [0x81495b9] **** v2 CLI RX| 80a9ae9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'MPL_New+0x182 [0x80a9ae9] **** v2 CLI RX| 80bb63d: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'SES_NewPool+0x13c [0x80bb63d] **** v2 CLI RX| 80afa47: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pool_mkpool+0x21a [0x80afa47] **** v2 CLI RX| 80afa9e: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pool_poolherder+0x41 [0x80afa9e] **** v2 CLI RX| fedfa97f: /lib/libc.so.1'_thrp_setup+0x7f [0xfedfa97f] **** v2 CLI RX| fedfac30: /lib/libc.so.1'_lwp_start+0x0 [0xfedfac30] **** v2 CLI RX|errno = 11 (Resource temporarily unavailable) **** v2 CLI RX|argv = { **** v2 CLI RX| [0] = \"vinyld\", **** v2 CLI RX| [1] = \"-d\", **** v2 CLI RX| [2] = \"-n\", **** v2 CLI RX| [3] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2\", **** v2 CLI RX| [4] = \"-i\", **** v2 CLI RX| [5] = \"v2\", **** v2 CLI RX| [6] = \"-l\", **** v2 CLI RX| [7] = \"2m\", **** v2 CLI RX| [8] = \"-p\", **** v2 CLI RX| [9] = \"auto_restart=off\", **** v2 CLI RX| [10] = \"-p\", **** v2 CLI RX| [11] = \"syslog_cli_traffic=off\", **** v2 CLI RX| [12] = \"-p\", **** v2 CLI RX| [13] = \"thread_pool_min=10\", **** v2 CLI RX| [14] = \"-p\", **** v2 CLI RX| [15] = \"debug=+vtc_mode\", **** v2 CLI RX| [16] = \"-p\", **** v2 CLI RX| [17] = \"vsl_mask=+Debug,+H2RxHdr,+H2RxBody\", **** v2 CLI RX| [18] = \"-p\", **** v2 CLI RX| [19] = \"h2_initial_window_size=1m\", **** v2 CLI RX| [20] = \"-p\", **** v2 CLI RX| [21] = \"h2_rx_window_low_water=64k\", **** v2 CLI RX| [22] = \"-a\", **** v2 CLI RX| [23] = \"127.0.0.1:0\", **** v2 CLI RX| [24] = \"-M\", **** v2 CLI RX| [25] = \"127.0.0.1 54624\", **** v2 CLI RX| [26] = \"-P\", **** v2 CLI RX| [27] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.405267.76cbfae7/v2/vinyld.pid\", **** v2 CLI RX| [28] = \"-p\", **** v2 CLI RX| [29] = \"vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:\", **** v2 CLI RX| [30] = \"-p\", **** v2 CLI RX| [31] = \"feature=+no_coredump\", **** v2 CLI RX| [32] = \"-p\", **** v2 CLI RX| [33] = \"vcc_feature=+allow_inline_c\", **** v2 CLI RX|} **** v2 CLI RX|pthread.self = 4 **** v2 CLI RX|pthread.name = (pool_poolherder) **** v2 CLI RX|thr.req = NULL **** v2 CLI RX|thr.busyobj = NULL **** v2 CLI RX|thr.worker = NULL **** v2 CLI RX|vmods = { **** v2 CLI RX|}, **** v2 CLI RX|pools = { **** v2 CLI RX|}, **** v2 CLI RX| **** v2 CLI RX| **** dT 6.792 ---- v2 Unexpected panic * top failure during reset # top TEST ../../../../bin/vinyltest/tests/c00057.vtc FAILED (6.795) exit=2 FAIL tests/c00057.vtc (exit status: 2)